**** dT 0.000 * top TEST ../../../../bin/vinyltest/vtest2/tests/a00007.vtc starting **** top extmacro def pkg_version=trunk **** top extmacro def pkg_branch=trunk **** top extmacro def pwd=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest **** top extmacro def date(...) **** top extmacro def string(...) **** top extmacro def localhost=127.0.0.1 **** top extmacro def bad_backend=127.0.0.1:49696 **** top extmacro def listen_addr=127.0.0.1:0 **** top extmacro def bad_ip=192.0.2.255 **** top extmacro def topbuild=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub **** top extmacro def topsrc=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/../.. **** top macro def testdir=/tmp/vtest.gcc13_m32_IPv4_uffix/varnish-cache/vinyl-cache-trunk/_build/sub/bin/vinyltest/../../../../bin/vinyltest/vtest2/tests **** top macro def tmpdir=/tmp/vtest.gcc13_m32_IPv4_uffix/_vtest_tmp/vtc.675781.6f57b6af **** top macro def vtcid=vtc.675781.6f57b6af ** top === vtest "TCP reuse" * top VTEST TCP reuse ** top === server s1 { ** top === server s1 -start ** s1 Starting server **** dT 0.001 **** s1 macro def s1_addr=127.0.0.1 **** s1 macro def s1_port=50112 **** s1 macro def s1_sock=127.0.0.1:50112 * s1 Listen on 127.0.0.1:50112 ** top === client c1 -connect ${s1_sock} { ** top === client c1 -run ** c1 Starting client **** dT 0.002 ** s1 Started on 127.0.0.1:50112 (1 iterations) ** c1 Waiting for client ** c1 Started on 127.0.0.1:50112 (1 iterations) *** c1 Connect to 127.0.0.1:50112 *** c1 connected fd 5 from 127.0.0.1 33268 to 127.0.0.1:50112 *** s1 accepted fd 4 127.0.0.1 33268 ** s1 === rxreq ** c1 === txreq -url "/1" -req "POST" -body "abcdefghi\n" **** c1 txreq|POST /1 HTTP/1.1\r **** c1 txreq|Host: 127.0.0.1\r **** c1 txreq|User-Agent: c1\r **** c1 txreq|Content-Length: 10\r **** c1 txreq|\r **** c1 txreq|abcdefghi ** c1 === rxresp **** s1 rxhdr|POST /1 HTTP/1.1\r **** s1 rxhdr|Host: 127.0.0.1\r **** s1 rxhdr|User-Agent: c1\r **** s1 rxhdr|Content-Length: 10\r **** s1 rxhdr|\r **** s1 rxhdrlen = 73 **** s1 http[ 0] |POST **** s1 http[ 1] |/1 **** s1 http[ 2] |HTTP/1.1 **** s1 http[ 3] |Host: 127.0.0.1 **** s1 http[ 4] |User-Agent: c1 **** s1 http[ 5] |Content-Length: 10 **** s1 c-l|abcdefghi **** s1 bodylen = 10 ** s1 === expect req.url == "/1" **** s1 EXPECT req.url (/1) == "/1" match ** s1 === txresp -body "123456789\n" **** s1 txresp|HTTP/1.1 200 OK\r **** s1 txresp|Date: Tue, 17 Mar 2026 02:50:18 GMT\r **** s1 txresp|Server: s1\r **** s1 txresp|Content-Length: 10\r **** s1 txresp|\r **** s1 txresp|123456789 ** s1 === rxreq **** dT 0.003 **** c1 rxhdr|HTTP/1.1 200 OK\r **** c1 rxhdr|Date: Tue, 17 Mar 2026 02:50:18 GMT\r **** c1 rxhdr|Server: s1\r **** c1 rxhdr|Content-Length: 10\r **** c1 rxhdr|\r **** c1 rxhdrlen = 88 **** c1 http[ 0] |HTTP/1.1 **** c1 http[ 1] |200 **** c1 http[ 2] |OK **** c1 http[ 3] |Date: Tue, 17 Mar 2026 02:50:18 GMT **** c1 http[ 4] |Server: s1 **** c1 http[ 5] |Content-Length: 10 **** c1 c-l|123456789 **** c1 bodylen = 10 ** c1 === txreq -url "/2" -req "POST" -body "ihgfedcba\n" **** c1 txreq|POST /2 HTTP/1.1\r **** c1 txreq|Host: 127.0.0.1\r **** c1 txreq|User-Agent: c1\r **** c1 txreq|Content-Length: 10\r **** c1 txreq|\r **** c1 txreq|ihgfedcba ** c1 === rxresp **** s1 rxhdr|POST /2 HTTP/1.1\r **** s1 rxhdr|Host: 127.0.0.1\r **** s1 rxhdr|User-Agent: c1\r **** s1 rxhdr|Content-Length: 10\r **** s1 rxhdr|\r **** s1 rxhdrlen = 73 **** s1 http[ 0] |POST **** s1 http[ 1] |/2 **** s1 http[ 2] |HTTP/1.1 **** s1 http[ 3] |Host: 127.0.0.1 **** s1 http[ 4] |User-Agent: c1 **** s1 http[ 5] |Content-Length: 10 **** s1 c-l|ihgfedcba **** s1 bodylen = 10 ** s1 === expect req.url == "/2" **** s1 EXPECT req.url (/2) == "/2" match ** s1 === txresp -body "987654321\n" **** s1 txresp|HTTP/1.1 200 OK\r **** s1 txresp|Date: Tue, 17 Mar 2026 02:50:18 GMT\r **** s1 txresp|Server: s1\r **** s1 txresp|Content-Length: 10\r **** s1 txresp|\r **** s1 txresp|987654321 *** s1 shutting fd 4 (server run) ** s1 Ending **** c1 rxhdr|HTTP/1.1 200 OK\r **** c1 rxhdr|Date: Tue, 17 Mar 2026 02:50:18 GMT\r **** c1 rxhdr|Server: s1\r **** c1 rxhdr|Content-Length: 10\r **** c1 rxhdr|\r **** c1 rxhdrlen = 88 **** c1 http[ 0] |HTTP/1.1 **** c1 http[ 1] |200 **** c1 http[ 2] |OK **** c1 http[ 3] |Date: Tue, 17 Mar 2026 02:50:18 GMT **** c1 http[ 4] |Server: s1 **** c1 http[ 5] |Content-Length: 10 **** c1 c-l|987654321 **** c1 bodylen = 10 *** c1 closing fd 5 ** c1 Ending ** top === server s1 -wait ** s1 Waiting for server (3/-1) * top RESETTING after ../../../../bin/vinyltest/vtest2/tests/a00007.vtc * top TEST ../../../../bin/vinyltest/vtest2/tests/a00007.vtc completed Assert error in cleaner_do(), ../../../../bin/vinyltest/vtest2/src/vtc_main.c line 240: Condition((system(buf)) == 0) not true. errno = 11 (Resource temporarily unavailable) ../../../../build-aux/test-driver: line 119: 675781: Abort FAIL vtest2/tests/a00007.vtc (exit status: 262)